[INFO] cloning repository https://github.com/Orkking2/UBQ
[INFO] running `Command { std: "git" "-c" "credential.helper=" "-c" "credential.helper=/workspace/cargo-home/bin/git-credential-null" "clone" "--bare" "https://github.com/Orkking2/UBQ" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FOrkking2%2FUBQ", kill_on_drop: false }`
[INFO] [stderr] Cloning into bare repository '/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FOrkking2%2FUBQ'...
[INFO] running `Command { std: "git" "rev-parse" "HEAD", kill_on_drop: false }`
[INFO] [stdout] f775e81b9273b2e0e8db41a4ea961f1f774c4ce9
[INFO] testing Orkking2/UBQ against try#28f95933dc0727396c07b48d0a8cb5211b7fb472 for pr-154065-2
[INFO] running `Command { std: "git" "clone" "/workspace/cache/git-repos/https%3A%2F%2Fgithub.com%2FOrkking2%2FUBQ" "/workspace/builds/worker-0-tc2/source", kill_on_drop: false }`
[INFO] [stderr] Cloning into '/workspace/builds/worker-0-tc2/source'...
[INFO] [stderr] done.
[INFO] started tweaking git repo https://github.com/Orkking2/UBQ
[INFO] finished tweaking git repo https://github.com/Orkking2/UBQ
[INFO] tweaked toml for git repo https://github.com/Orkking2/UBQ written to /workspace/builds/worker-0-tc2/source/Cargo.toml
[INFO] validating manifest of git repo https://github.com/Orkking2/UBQ on toolchain 28f95933dc0727396c07b48d0a8cb5211b7fb472
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--manifest-path" "Cargo.toml" "--no-deps", kill_on_drop: false }`
[INFO] crate git repo https://github.com/Orkking2/UBQ already has a lockfile, it will not be regenerated
[INFO] running `Command { std: CARGO_HOME="/workspace/cargo-home" RUSTUP_HOME="/workspace/rustup-home" "/workspace/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "fetch" "--manifest-path" "Cargo.toml", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "metadata" "--no-deps" "--format-version=1", kill_on_drop: false }`
[INFO] [stdout] c68e62b58dc42964c3012c4c23bca30a2c4a15340d9bb0ce4e92359aef01789e
[INFO] running `Command { std: "docker" "start" "-a" "c68e62b58dc42964c3012c4c23bca30a2c4a15340d9bb0ce4e92359aef01789e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "inspect" "c68e62b58dc42964c3012c4c23bca30a2c4a15340d9bb0ce4e92359aef01789e", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "c68e62b58dc42964c3012c4c23bca30a2c4a15340d9bb0ce4e92359aef01789e", kill_on_drop: false }`
[INFO] [stdout] c68e62b58dc42964c3012c4c23bca30a2c4a15340d9bb0ce4e92359aef01789e
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "build" "--frozen" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 7d4c13028f33e29967a91ca51ac96ebfc9f681fcaabedb099fe57ae9f606ae9b
[INFO] running `Command { std: "docker" "start" "-a" "7d4c13028f33e29967a91ca51ac96ebfc9f681fcaabedb099fe57ae9f606ae9b", kill_on_drop: false }`
[INFO] [stderr]    Compiling proc-macro2 v1.0.103
[INFO] [stderr]    Compiling quote v1.0.42
[INFO] [stderr]    Compiling unicode-ident v1.0.22
[INFO] [stderr]    Compiling is_terminal_polyfill v1.70.2
[INFO] [stderr]    Compiling anstyle-query v1.1.5
[INFO] [stderr]    Compiling hashbrown v0.16.1
[INFO] [stderr]    Compiling colorchoice v1.0.5
[INFO] [stderr]    Compiling anstyle v1.0.14
[INFO] [stderr]    Compiling clap_lex v1.1.0
[INFO] [stderr]    Compiling anstyle-parse v0.2.7
[INFO] [stderr]    Compiling toml_write v0.1.2
[INFO] [stderr]    Compiling num_cpus v1.17.0
[INFO] [stderr]    Compiling ubq v4.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]    Compiling memchr v2.7.6
[INFO] [stderr]    Compiling tokio v1.50.0
[INFO] [stderr]    Compiling core_affinity v0.8.3
[INFO] [stderr]    Compiling anstream v0.6.21
[INFO] [stderr]    Compiling serde_json v1.0.145
[INFO] [stderr]    Compiling clap_builder v4.5.60
[INFO] [stderr]    Compiling indexmap v2.13.0
[INFO] [stderr]    Compiling syn v2.0.111
[INFO] [stderr]    Compiling serde_derive v1.0.228
[INFO] [stderr]    Compiling clap_derive v4.5.55
[INFO] [stderr]    Compiling clap v4.5.60
[INFO] [stderr]    Compiling serde v1.0.228
[INFO] [stderr]    Compiling serde_spanned v0.6.9
[INFO] [stderr]    Compiling toml_datetime v0.6.11
[INFO] [stderr]    Compiling toml_edit v0.22.27
[INFO] [stderr]    Compiling toml v0.8.23
[INFO] [stderr]     Finished `dev` profile [unoptimized + debuginfo] target(s) in 24.31s
[INFO] running `Command { std: "docker" "inspect" "7d4c13028f33e29967a91ca51ac96ebfc9f681fcaabedb099fe57ae9f606ae9b", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "7d4c13028f33e29967a91ca51ac96ebfc9f681fcaabedb099fe57ae9f606ae9b", kill_on_drop: false }`
[INFO] [stdout] 7d4c13028f33e29967a91ca51ac96ebfc9f681fcaabedb099fe57ae9f606ae9b
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen" "--no-run" "--message-format=json", kill_on_drop: false }`
[INFO] [stdout] 5c1513bc36962b03b0ed96e4c4f1a82022f18a71a870ea7081ee8d19960da895
[INFO] running `Command { std: "docker" "start" "-a" "5c1513bc36962b03b0ed96e4c4f1a82022f18a71a870ea7081ee8d19960da895", kill_on_drop: false }`
[INFO] [stderr]    Compiling ubq v4.0.0 (/opt/rustwide/workdir)
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 5.18s
[INFO] running `Command { std: "docker" "inspect" "5c1513bc36962b03b0ed96e4c4f1a82022f18a71a870ea7081ee8d19960da895", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "5c1513bc36962b03b0ed96e4c4f1a82022f18a71a870ea7081ee8d19960da895", kill_on_drop: false }`
[INFO] [stdout] 5c1513bc36962b03b0ed96e4c4f1a82022f18a71a870ea7081ee8d19960da895
[INFO] running `Command { std: "docker" "create" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/target:/opt/rustwide/target:rw,Z" "-v" "/var/lib/crater-agent-workspace/builds/worker-0-tc2/source:/opt/rustwide/workdir:ro,Z" "-v" "/var/lib/crater-agent-workspace/cargo-home:/opt/rustwide/cargo-home:ro,Z" "-v" "/var/lib/crater-agent-workspace/rustup-home:/opt/rustwide/rustup-home:ro,Z" "-e" "SOURCE_DIR=/opt/rustwide/workdir" "-e" "CARGO_TARGET_DIR=/opt/rustwide/target" "-e" "CARGO_INCREMENTAL=0" "-e" "RUST_BACKTRACE=full" "-e" "RUSTFLAGS=--cap-lints=forbid" "-e" "RUSTDOCFLAGS=--cap-lints=forbid" "-e" "CARGO_HOME=/opt/rustwide/cargo-home" "-e" "RUSTUP_HOME=/opt/rustwide/rustup-home" "-w" "/opt/rustwide/workdir" "-m" "1610612736" "--user" "0:0" "--network" "none" "ghcr.io/rust-lang/crates-build-env/linux@sha256:d429b63d4308055ea97f60fb1d3dfca48854a00942f1bd2ad806beaf015945ec" "/opt/rustwide/cargo-home/bin/cargo" "+28f95933dc0727396c07b48d0a8cb5211b7fb472" "test" "--frozen", kill_on_drop: false }`
[INFO] [stdout] 933b6fdc6bc9297f1dc6f0922879d924063e547acc78a2b870f98f97cec12cb6
[INFO] running `Command { std: "docker" "start" "-a" "933b6fdc6bc9297f1dc6f0922879d924063e547acc78a2b870f98f97cec12cb6", kill_on_drop: false }`
[INFO] [stderr]     Finished `test` profile [unoptimized + debuginfo] target(s) in 0.10s
[INFO] [stderr]      Running unittests src/lib.rs (/opt/rustwide/target/debug/deps/ubq-aee33af358f7924f)
[INFO] [stdout] 
[INFO] [stdout] running 43 tests
[INFO] [stdout] test bench_harness::tests::app_log_mpsc_file_requires_one_consumer ... ok
[INFO] [stdout] test bench_harness::tests::direct_plan_expands_fastfifo_block_variants ... ok
[INFO] [stdout] test bench_harness::tests::direct_plan_expands_publication_queue_variants ... ok
[INFO] [stdout] test bench_harness::tests::direct_plan_requires_ubq_labels_if_ubq_selected ... ok
[INFO] [stdout] test bench_harness::tests::direct_plan_omits_wcq_fill_drain_when_capacity_cannot_hold_prefill ... ok
[INFO] [stdout] test bench_harness::tests::direct_plan_skips_labels_incompatible_with_scenario ... ok
[INFO] [stdout] test bench_harness::tests::direct_plan_schedules_application_modes_but_excludes_wcq ... ok
[INFO] [stdout] test bench_harness::tests::frontier_bootstraps_seed_across_all_scenarios ... ok
[INFO] [stdout] test bench_harness::tests::frontier_does_not_propagate_winner_invalid_for_scenario ... ok
[INFO] [stdout] test bench_harness::tests::frontier_expands_local_winners_only ... ok
[INFO] [stdout] test bench_harness::tests::frontier_runs_local_winner_across_all_scenarios ... ok
[INFO] [stdout] test bench_harness::tests::parses_application_metric_modes ... ok
[INFO] [stdout] test bench_harness::tests::parses_fastfifo_aliases_and_block_sizes ... ok
[INFO] [stdout] test bench_harness::tests::frontier_expands_local_best_ubq_even_when_baseline_wins ... ok
[INFO] [stdout] test bench_harness::tests::frontier_does_not_expand_nonbest_baseline_beater ... ok
[INFO] [stdout] test bench_harness::tests::parses_bbq_atc22_scenario_selectors ... ok
[INFO] [stdout] test bench_harness::tests::scenario_search_excludes_small_blocks_for_high_producer_count ... ok
[INFO] [stdout] test bench_harness::tests::scheduler_allows_jobs_until_thread_budget_is_exhausted ... ok
[INFO] [stdout] test bench_harness::tests::serialization_omits_none_fields ... ok
[INFO] [stdout] test tests::configured_queue_supports_arbitrary_block_with_explicit_alignment ... ok
[INFO] [stdout] test bench_harness::tests::frontier_expands_when_wcq_is_unsupported_for_one_mode ... ok
[INFO] [stdout] test bench_harness::tests::parses_four_part_ubq_labels ... ok
[INFO] [stdout] test bench_harness::tests::log_meta_roundtrips_and_writer_renders_line ... ok
[INFO] [stdout] test bench_harness::tests::frontier_rejects_scenarios_without_valid_seed_labels ... ok
[INFO] [stdout] test bench_harness::tests::incremental_writer_persists_partial_bundle_snapshots ... ok
[INFO] [stdout] test tests::ubq_macro_applies_explicit_overrides ... ok
[INFO] [stdout] test tests::ubq_macro_defaults_to_public_alias ... ok
[INFO] [stdout] test tests::ubq_macro_supports_custom_alignment_override ... ok
[INFO] [stdout] test bench_harness::tests::parses_publication_queue_aliases_and_sizes ... ok
[INFO] [stdout] test bench_harness::tests::parses_machine_mpsc_scenarios_with_reserved_writer ... ok
[INFO] [stdout] test bench_harness::tests::parses_bbq_atc22_metric_modes ... ok
[INFO] [stdout] test tests::configured_queue_supports_non_default_pool_and_preset_block ... ok
[INFO] [stdout] test bench_harness::tests::execute_job_factories_can_run_multiple_ubq_jobs_concurrently ... ok
[INFO] [stdout] test tests::drop_releases_all_enqueued_values ... ok
[INFO] [stdout] test bench_harness::tests::scenario_search_includes_zero_pool_counterpart_for_nonzero_pool ... ok
[INFO] [stdout] test bench_harness::tests::execute_job_factories_writes_cached_bundles_without_pending_jobs ... ok
[INFO] [stdout] test bench_harness::tests::execute_job_factories_records_timeout_and_continues ... ok
[INFO] [stdout] test bench_harness::tests::application_modes_complete_small_segqueue_runs ... ok
[INFO] [stdout] test tests::refill_drain_recycled_blocks ... ok
[INFO] [stdout] test tests::fill_drain_ordered ... ok
[INFO] [stdout] test tests::mpmc ... ok
[INFO] [stdout] test tests::push_test ... ok
[INFO] [stdout] test bench_harness::tests::app_log_mpsc_file_completes_small_segqueue_run has been running for over 60 seconds
[ERROR] error running command: no output for 300 seconds
[INFO] running `Command { std: "docker" "inspect" "933b6fdc6bc9297f1dc6f0922879d924063e547acc78a2b870f98f97cec12cb6", kill_on_drop: false }`
[INFO] running `Command { std: "docker" "rm" "-f" "933b6fdc6bc9297f1dc6f0922879d924063e547acc78a2b870f98f97cec12cb6", kill_on_drop: false }`
[INFO] [stdout] 933b6fdc6bc9297f1dc6f0922879d924063e547acc78a2b870f98f97cec12cb6
